Chrome


Overall Result: Pass
------------------------------------------------------------
'21.02.2017 16:41:55' - Executing test: 'Login', path: 'Login.tstest.'
'21.02.2017 16:41:55' - Using .Net Runtime version: '4.0.30319.42000' for test execution. Build version is '2017.1.207.0'.
'21.02.2017 16:41:55' - Starting execution....
------------------------------------------------------------
------------------------------------------------------------
'21.02.2017 16:41:59' - Using 'Chrome' version '56.0.2924.87' as default browser. 
'21.02.2017 16:41:59' - Using 'http://vm-XXXX-XXX.profinit.lab:8020' as base url.
'21.02.2017 16:42:24' - 'Pass' : 1. Navigate to : 'http://vm-XXXX-XXX.profinit.lab:8020'
'21.02.2017 16:42:24' - 'Pass' : 2. Handle 'Logon' dialog.
------------------------------------------------------------
'21.02.2017 16:42:24' - Overall Result: Pass
'21.02.2017 16:42:24' - Duration: [0 min: 24 sec: 621 msec]
------------------------------------------------------------
'21.02.2017 16:42:24' - Test completed!





[02.21 16:41:54,ArtOfTest.Runner.exe(14988:3)] First trace message from process 14988: "C:\Program Files (x86)\Telerik\Test Studio\Bin\ArtOfTest.Runner.exe"  /controller /parentprocesshandle=6608
[02.21 16:41:54,ArtOfTest.Runner.exe(14988:3)] First trace message from foreground thread "Remote.ArtOfTest.Runner.Listener" (managed ID = 3, native ID = 13452).
[02.21 16:41:54,ArtOfTest.Runner.exe(14988:3),TestStudio] Loader.LoadTranslatorGroups() : ------- Function Start -------
[02.21 16:41:55,ArtOfTest.Runner.exe(14988:3),TestStudio] Loader.LoadTranslatorGroups() : ------- Function End -------
[02.21 16:41:55,Telerik.TestStudio.Desktop.exe(224:1),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[02.21 16:41:57,Telerik.TestStudio.Desktop.exe(224:1),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[02.21 16:41:58,ArtOfTest.Runner.exe(14988:9)] First trace message from pool unnamed thread (managed ID = 9, native ID = 8092).
[02.21 16:41:58,ArtOfTest.Runner.exe(14988:9),Framework] Manager.AddNewBrowser() : Added client ID "a9fc0238-c32f-4946-bcda-bf8372dce5f8" (now there is/are 1 total).
[02.21 16:41:59,Telerik.TestStudio.Desktop.exe(224:1),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[02.21 16:41:59,Telerik.TestStudio.Desktop.exe(224:1),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4)] First trace message from pool unnamed thread (managed ID = 4, native ID = 10044).
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Execution] ExecutionEngine.InternalExecuteTest() : Executing test: 'Login', path: 'Login.tstest.'
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Execution] ExtensionsManager.LoadExtensions() : ------- Function Start -------
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Uncategorized] ExtensionsManager.LoadExtensions() : Got 15 plugin(s) in folder "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins".
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "LibGit2Sharp.dll" from plugins folder.
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Functional.dll" from plugins folder.
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Jira.BugTracking.dll" from plugins folder.
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Load.dll" from plugins folder.
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Manual.dll" from plugins folder.
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.OTA.Interop.dll" from plugins folder.
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Plugins.dll" from plugins folder.
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.ProductGuide.dll" from plugins folder.
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Shared.dll" from plugins folder.
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.SourceControl.dll" from plugins folder.
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.SourceControl.Git.dll" from plugins folder.
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.SourceControl.Git.TS.dll" from plugins folder.
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.TeamPulse.dll" from plugins folder.
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Web.dll" from plugins folder.
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Wpf.dll" from plugins folder.
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Execution] ExtensionsManager.LoadExtensions() : ------- Function End -------
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),TestStudio] VisualDebugger.SetCurrentResult() : VisualDebugger::SetCurrentResult
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),DialogPlayback] DialogMonitor.Start() : Beginning monitoring for dialogs from the set {}.
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[02.21 16:41:59,ArtOfTest.Runner.exe(14988:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 1 "Navigate to : 'http://vm-XXXX-XXX.profinit.lab:8020'"...
[02.21 16:42:00,ArtOfTest.Runner.exe(14988:7)] First trace message from background thread "UAI Dispatcher Thread" (managed ID = 7, native ID = 14116).
[02.21 16:42:00,ArtOfTest.Runner.exe(14988:7),DialogPlayback] DialogMonitor.HandleElement() : LogonDialog(UserName=tester,Password=*******,Dismiss=OK) detected, now attempting to handle it.
[02.21 16:42:03,ArtOfTest.Runner.exe(14988:7),DialogPlayback] DialogMonitor.HandleElement() : LogonDialog(UserName=tester,Password=*******,Dismiss=OK) handled.
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),Error] Browser.StartAjaxListener() : EXCEPTION! (see below)
     Situation: Unable to Invoke the Ajax Listener script
     Outer Exception Type: System.TimeoutException
     Message: Wait for condition has timed out
     HRESULT: 0x80131505 (Official ID (if app.) = COR_E_TIMEOUT, Error Bit = FAILED, Facility = FACILITY_URT, Code = 5381)
     Call Stack:
          at ArtOfTest.Common.WaitSync.CheckResult(WaitSync wait, String extraExceptionInfo, Object target)
          at ArtOfTest.Common.WaitSync.For[T](Predicate`1 predicate, T target, Boolean invertCondition, Int32 timeout, WaitResultType errorResultType)
          at ArtOfTest.Common.WaitSync.For[T](Predicate`1 predicate, T target, Boolean invertCondition, Int32 timeout)
          at ArtOfTest.WebAii.Core.Browser.WaitUntilReady()
          at ArtOfTest.WebAii.Core.Browser.ExecuteCommand(BrowserCommand request, Boolean performDomRefresh, Boolean waitUntilReady)
          at ArtOfTest.WebAii.Core.Browser.ExecuteCommand(BrowserCommand request)
          at ArtOfTest.WebAii.Core.Actions.InvokeScript(String script)
          at ArtOfTest.WebAii.Core.Browser.StartAjaxListener()

[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 1 "Navigate to : 'http://vm-XXXX-XXX.profinit.lab:8020'".
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 2 "Handle 'Logon' dialog."...
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),DialogPlayback] BaseDialog.WaitUntilAnyHandled() : Beginning 5000 msec wait for any dialog from the set to be handled {LogonDialog(UserName=tester,Password=*******,Dismiss=OK)}.
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),DialogPlayback] BaseDialog.WaitUntilAnyHandled() : LogonDialog(UserName=tester,Password=*******,Dismiss=OK) handling was detected after 0 msec.
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 2 "Handle 'Logon' dialog.".
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::Start
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::ShutDown::Start
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::DetachWrappedWindow::Start
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::DetachWrappedWindow::End
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::DispatcherBeginInvokeShutdown::Start
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::Close::Start
[02.21 16:42:24,ArtOfTest.Runner.exe(14988:4),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::End
